[2013.07.28 18:23:09] [0000m.00s.015ms] [0] WELCOME
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] iCDB Server ver.1.094, a0HSsGQ+3llE3aODnNgIUw, build:515009 created 2012-08-09 08:10:43, sources stamp:a0HSsGQ+3llE3aODnNgIUw
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] Copyright 2012 Mentor Graphics Corporation. All Rights Reserved.
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] Base flow version [7.9.4]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] GBS Install Id [26418], Flow Id [EE7.9.4], Full Flow Name [Expedition Enterprise Flow], Exact Access Date [Jun 1 2012]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] Machine [CAD0]  User [lev]  PID [3324]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] Operating system [Microsoft Windows XP Professional Service Pack 3 (build 2600)]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] Current working dir [Y:\Boards\VB\NEW_Project\PCB]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] PATH [C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\xe\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\wg\win32\lib;C:\Program Files\NVIDIA Corporation\PhysX\Common;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\MGC_HOME.ixn\bin;C:\MentorGraphics\7.9.4EE\MGC_HOME.ixn\lib;C:\Cadence\SPB_16.5\OpenAccess\bin\win32\opt;C:\Cadence\SPB_16.5\tools\Capture;C:\Cadence\SPB_16.5\tools\PSpice\Library;C:\Cadence\SPB_16.5\tools\PSpice;C:\Cadence\SPB_16.5\tools\specctra\bin;C:\Cadence\SPB_16.5\tools\fet\bin;C:\Cadence\SPB_16.5\tools\libutil\bin;C:\Cadence\SPB_16.5\tools\bin;C:\Cadence\SPB_16.5\tools\pcb\bin;C:\Program Files\Common Files\ArcSoft\Bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Common Files\Roxio Shared\DLLShared;C:\Program Files\Common Files\Acronis\SnapAPI\;C:\MentorGraphics\Allegro Export ODB++\nv\bin;]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] SDD_HOME [C:\MentorGraphics\7.9.4EE\SDD_HOME] on file system [NTFS]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] SDD_PLATFORM [win32]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] WDIR [C:\MentorGraphics;C:\MentorGraphics\7.9.4EE\SDD_HOME\standard]
[2013.07.28 18:23:09] [0000m.00s.015ms] [1] Local iCDB working dir [C:\MentorGraphics\iCDB] on file system [NTFS]
[2013.07.28 18:23:09] [0000m.00s.031ms] [1] S: Config file name [ServerWG.cfg]
[2013.07.28 18:23:09] [0000m.00s.031ms] [2] S: Loading config files
[2013.07.28 18:23:09] [0000m.00s.031ms] [1] Config file [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb\cdbsvr\ServerWG.cfg] not found
[2013.07.28 18:23:09] [0000m.00s.031ms] [1] Config: Non-default value [System.SingleUserMode] = [no]
[2013.07.28 18:23:09] [0000m.00s.031ms] [3] S: Config loaded
[2013.07.28 18:23:09] [0000m.00s.031ms] [0] S: Project path [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb] on file system [NTFS]
[2013.07.28 18:23:09] [0000m.00s.031ms] [0] S: Project global path [\\Server\Projects\Boards\VB\NEW_Project\PCB\keyin.icdb] on file system [UNKNOWN]
[2013.07.28 18:23:09] [0000m.00s.031ms] [0] S: Project file (.prj) path [\\Server\Projects\Boards\VB\NEW_Project\PCB\template.prj] on file system [UNKNOWN]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Project file (.prj) local path [Y:\Boards\VB\NEW_Project\PCB\template.prj] on file system [NTFS]
[2013.07.28 18:23:09] [0000m.00s.046ms] [1] S: WARNING: Database auto-repair support DISABLED
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Multi-user mode (config)
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Event polling mode autodetection
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Started up automatically by iCDB Client: CAD0:lev:4124
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Auto close mode
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Database ID [85ed-da58-ef7e-5c19-a573-5f1f-5735-f150-f2ce-fd2c-1646-86c5]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: BEGIN dumping
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: Local -> global path prefix list
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [U:\] -> [\\server\Install\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [V:\] -> [\\Server\Management\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [W:\] -> [\\Sqlserver\AppDistribution\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [X:\] -> [\\Server\CAD0\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [Y:\] -> [\\Server\Projects\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [Z:\] -> [\\Server\Software\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: Global -> local path prefix list
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [\\Sqlserver\AppDistribution\] -> [W:\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [\\Server\Management\] -> [V:\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [\\Server\Projects\] -> [Y:\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [\\Server\Software\] -> [Z:\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [\\server\Install\] -> [U:\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: [\\Server\CAD0\] -> [X:\]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] PathTranslator: END dumping
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: START
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Server startup lock file created
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Listening for client connections on port [10001]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Server network ID [CAD0:192.168.1.26,CAD0,CAD0.valigent.local:10001]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Server GUID [4dc4-5f07-d21a-aef3-d573-5f12-6735-f150-f10f-fd2c-1646-86c5]
[2013.07.28 18:23:09] [0000m.00s.046ms] [0] S: Project GUID [85ed-da58-ef7e-5c19-a573-5f1f-5735-f150-f2ce-fd2c-1646-86c5]
[2013.07.28 18:23:09] [0000m.00s.062ms] [0] S: Wrote data to server address file
[2013.07.28 18:23:09] [0000m.00s.062ms] [0] S: Server startup lock file removed
[2013.07.28 18:23:09] [0000m.00s.062ms] [1] ProjectBackupManager: Setting project file (.prj) path: [Y:\Boards\VB\NEW_Project\PCB\template.prj]
[2013.07.28 18:23:09] [0000m.00s.125ms] [0] S: Plugins loaded: [PIM] [ENetGen70] 
[2013.07.28 18:23:09] [0000m.00s.125ms] [0] S: Local disc access time: 26 us
[2013.07.28 18:23:09] [0000m.00s.125ms] [0] S: File server access time: 463 us
[2013.07.28 18:23:09] [0000m.00s.125ms] [0] S: Server will not release in-memory storage after read (memory usage overhead) - for better performance
[2013.07.28 18:23:09] [0000m.00s.125ms] [0] Single file [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb\icdb.dat] size [54128 (52.9 kB)]
[2013.07.28 18:23:09] [0000m.00s.125ms] [1] Single file [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb\icdb.dat] opened in read-write mode
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] Database GUARD OK: [54128]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] Database GUARD OK: [54128]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] SingleFile: [1e10-38a3-6df9-d43f] SFI version check [1009] [1009]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] SingleFile: [1e10-38a3-6df9-d43f] Database SFI header has been read in [654us]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] iCDB Server PI: Server & plugin session [3]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] iCDB Server PI: Opening database [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb]
[2013.07.28 18:23:09] [0000m.00s.140ms] [0] iCDB Server PI: Database [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb] opened
[2013.07.28 18:23:09] [0000m.00s.156ms] [0] iCDB Database: Checking existence of constraint definitions
[2013.07.28 18:23:09] [0000m.00s.156ms] [0] iCDB Database: Checking constraint definitions version
[2013.07.28 18:23:09] [0000m.00s.203ms] [1] iCDB Database: Constraint definitions version [ce_ee.cns=7.10.24;user.cns=1d2f-2dbf-00b9-0ed4-56e9-161a-6e91-6150-796e-fd2c-1646-86c5] up to date
[2013.07.28 18:23:09] [0000m.00s.234ms] [0] iCDB Server PI: Initializing plugins
[2013.07.28 18:23:09] [0000m.00s.234ms] [0] iCDB Server PI: Plugins initialized
[2013.07.28 18:23:09] [0000m.00s.234ms] [0] S: iCDB database loaded
[2013.07.28 18:23:09] [0000m.00s.234ms] [0] S: Starting threads
[2013.07.28 18:23:09] [0000m.00s.234ms] [1] CMT: There are no clients - waiting [10 seconds]
[2013.07.28 18:23:09] [0000m.00s.234ms] [0] BT: Listening for broadcast messages on port [10000]
[2013.07.28 18:23:09] [0000m.00s.234ms] [0] IT: Session [4] for host [CAD0] user [lev] with process ID [4124] created
[2013.07.28 18:23:09] [0000m.00s.234ms] [1] SC[4]: Registered sub-client [Expedition PCB_32385906] with ID [1] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:23:10] [0000m.00s.343ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:23:10] [0000m.01s.000ms] [1] PrjBackupMgr: Successfully created Project Backup [Y:\Boards\VB\NEW_Project\PCB\ProjectBackup\backups\2013-07-28 18.23.09 - auto.zip] with GUID [3617-a811-70ff-7085-d573-5f12-6735-f150-f8be-fd2c-1646-86c5]
[2013.07.28 18:23:10] [0000m.01s.000ms] [0] PrjBackupEngine: Successfully created backup:  BackupGUID[3617-a811-70ff-7085-d573-5f12-6735-f150-f8be-fd2c-1646-86c5] CreationTime[Sunday, July 28, 2013 15:23:09] Type[Autosave] Creator[iCDB Server (2013-07-28 18.23.09-3324)] ApplicationName[iCDB Server (2013-07-28 18.23.09-3324)] UserName[lev] MachineName[CAD0] Description[Autosave] FullFlowName[Expedition Enterprise Flow] FlowId[EE7.9.4] GBSInstallId[26418] GBSBuildId[515009] IcdbVersion[2709] ReferenceLogFilePath[] BackupFilePath[Y:\Boards\VB\NEW_Project\PCB\ProjectBackup\backups\2013-07-28 18.23.09 - auto.zip] BackupFileSize[314393] Persistent[FALSE]
[2013.07.28 18:23:39] [0000m.29s.921ms] [0] DFAMT: File server access time: 541 us
[2013.07.28 18:23:46] [0000m.37s.171ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32423109] with ID [2] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:23:46] [0000m.37s.171ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32423109] with ID [2] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:23:47] [0000m.37s.906ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32423843] with ID [3] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:23:47] [0000m.37s.984ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32423843] with ID [3] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:24:48] [0001m.39s.203ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32485156] with ID [4] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:24:48] [0001m.39s.234ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32485156] with ID [4] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:25:07] [0001m.58s.156ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32504093] with ID [5] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:25:07] [0001m.58s.156ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32504093] with ID [5] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:25:08] [0001m.58s.921ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32504875] with ID [6] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:25:08] [0001m.59s.015ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32504875] with ID [6] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:25:27] [0002m.17s.468ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32523406] with ID [7] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:25:27] [0002m.17s.484ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32523406] with ID [7] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:30:52] [0007m.42s.578ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32848531] with ID [8] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:30:52] [0007m.42s.640ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_32848578] with ID [9] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:30:52] [0007m.42s.843ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32848531] with ID [8] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:30:52] [0007m.42s.859ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_32848578] with ID [9] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:35:46] [0012m.36s.968ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33142921] with ID [10] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:35:46] [0012m.36s.984ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33142921] with ID [10] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:35:46] [0012m.37s.031ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33142968] with ID [11] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:35:46] [0012m.37s.046ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33142968] with ID [11] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:35:47] [0012m.37s.500ms] [0] IT: Session [5] for host [CAD0] user [lev] with process ID [5992] created
[2013.07.28 18:35:47] [0012m.37s.500ms] [1] SC[5]: Registered sub-client [JobPrefsDBPI_33143421] with ID [1] for session ID [5] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:47] [0012m.37s.515ms] [1] SC[5]: UnRegistered sub-client [JobPrefsDBPI_33143421] with ID [1] for session ID [5] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:47] [0012m.37s.546ms] [1] CMT: There are [2] clients now: 4, 5
[2013.07.28 18:35:47] [0012m.37s.546ms] [1] CMT: Removed client [5]
[2013.07.28 18:35:47] [0012m.37s.546ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:35:47] [0012m.38s.093ms] [0] IT: Session [6] for host [CAD0] user [lev] with process ID [5992] created
[2013.07.28 18:35:47] [0012m.38s.093ms] [1] SC[6]: Registered sub-client [JobPrefsDBPI_33144015] with ID [1] for session ID [6] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:47] [0012m.38s.140ms] [1] SC[6]: Registered sub-client [JobPrefsDBPI_33144093] with ID [2] for session ID [6] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:47] [0012m.38s.156ms] [1] SC[6]: UnRegistered sub-client [JobPrefsDBPI_33144015] with ID [1] for session ID [6] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:47] [0012m.38s.171ms] [1] SC[6]: UnRegistered sub-client [JobPrefsDBPI_33144093] with ID [2] for session ID [6] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:47] [0012m.38s.203ms] [1] CMT: There are [2] clients now: 4, 6
[2013.07.28 18:35:47] [0012m.38s.203ms] [1] CMT: Removed client [6]
[2013.07.28 18:35:47] [0012m.38s.203ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:35:48] [0012m.38s.671ms] [0] IT: Session [7] for host [CAD0] user [lev] with process ID [5992] created
[2013.07.28 18:35:48] [0012m.38s.671ms] [1] SC[7]: Registered sub-client [JobPrefsDBPI_33144578] with ID [1] for session ID [7] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:48] [0012m.38s.734ms] [1] SC[7]: Registered sub-client [JobPrefsDBPI_33144687] with ID [2] for session ID [7] host [CAD0] user [lev] process ID [5992]
[2013.07.28 18:35:48] [0012m.38s.750ms] [1] CMT: There are [2] clients now: 4, 7
[2013.07.28 18:35:54] [0012m.44s.578ms] [0] SC[7]: ERROR: Receiving command: Socket Exception: Category[Socket] Error[ReceiveFailed] Description[Could not receive data from peer; ECONNRESET - Connection reset by peer.] Message[Receiving network command with timeout]
[2013.07.28 18:35:54] [0012m.44s.578ms] [0] SC[7]: Setting status to OFFLINE
[2013.07.28 18:35:54] [0012m.44s.656ms] [1] CMT: Trying to remove local offline client [7]
[2013.07.28 18:35:54] [0012m.44s.656ms] [0] CRT[7]: EXIT: Because of client death
[2013.07.28 18:35:54] [0012m.44s.656ms] [1] CMT: Removed local offline client [7]
[2013.07.28 18:35:54] [0012m.44s.656ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:13] [0014m.03s.343ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33229296] with ID [12] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:13] [0014m.03s.406ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33229343] with ID [13] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:13] [0014m.03s.578ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33229296] with ID [12] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:13] [0014m.03s.593ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33229343] with ID [13] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:34] [0014m.25s.281ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33251234] with ID [14] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:35] [0014m.25s.296ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33251234] with ID [14] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:35] [0014m.25s.343ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33251281] with ID [15] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:35] [0014m.25s.359ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33251281] with ID [15] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:35] [0014m.25s.750ms] [0] IT: Session [8] for host [CAD0] user [lev] with process ID [4808] created
[2013.07.28 18:37:35] [0014m.25s.750ms] [1] SC[8]: Registered sub-client [JobPrefsDBPI_33251625] with ID [1] for session ID [8] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:35] [0014m.25s.765ms] [1] SC[8]: UnRegistered sub-client [JobPrefsDBPI_33251625] with ID [1] for session ID [8] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:35] [0014m.25s.828ms] [1] CMT: There are [2] clients now: 4, 8
[2013.07.28 18:37:35] [0014m.25s.828ms] [1] CMT: Removed client [8]
[2013.07.28 18:37:35] [0014m.25s.828ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:36] [0014m.26s.343ms] [0] IT: Session [9] for host [CAD0] user [lev] with process ID [4808] created
[2013.07.28 18:37:36] [0014m.26s.343ms] [1] SC[9]: Registered sub-client [JobPrefsDBPI_33252250] with ID [1] for session ID [9] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:36] [0014m.26s.375ms] [1] CMT: There are [2] clients now: 4, 9
[2013.07.28 18:37:36] [0014m.26s.375ms] [1] SC[9]: Registered sub-client [JobPrefsDBPI_33252328] with ID [2] for session ID [9] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:36] [0014m.26s.390ms] [1] SC[9]: UnRegistered sub-client [JobPrefsDBPI_33252250] with ID [1] for session ID [9] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:36] [0014m.26s.390ms] [1] SC[9]: UnRegistered sub-client [JobPrefsDBPI_33252328] with ID [2] for session ID [9] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:36] [0014m.26s.484ms] [1] CMT: Removed client [9]
[2013.07.28 18:37:36] [0014m.26s.484ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:36] [0014m.26s.906ms] [0] IT: Session [10] for host [CAD0] user [lev] with process ID [4808] created
[2013.07.28 18:37:36] [0014m.26s.906ms] [1] SC[10]: Registered sub-client [JobPrefsDBPI_33252828] with ID [1] for session ID [10] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:36] [0014m.26s.921ms] [1] CMT: There are [2] clients now: 4, 10
[2013.07.28 18:37:36] [0014m.26s.968ms] [1] SC[10]: Registered sub-client [JobPrefsDBPI_33252906] with ID [2] for session ID [10] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:37] [0014m.27s.296ms] [1] SC[10]: UnRegistered sub-client [JobPrefsDBPI_33252906] with ID [2] for session ID [10] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:37] [0014m.27s.296ms] [1] SC[10]: UnRegistered sub-client [JobPrefsDBPI_33252828] with ID [1] for session ID [10] host [CAD0] user [lev] process ID [4808]
[2013.07.28 18:37:37] [0014m.27s.359ms] [1] CMT: Removed client [10]
[2013.07.28 18:37:37] [0014m.27s.359ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:37] [0014m.27s.453ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33253406] with ID [16] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:37] [0014m.27s.468ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33253406] with ID [16] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:55] [0014m.46s.171ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33272125] with ID [17] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:55] [0014m.46s.187ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33272125] with ID [17] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:55] [0014m.46s.234ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33272171] with ID [18] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:55] [0014m.46s.250ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33272171] with ID [18] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:56] [0014m.46s.593ms] [0] IT: Session [11] for host [CAD0] user [lev] with process ID [3024] created
[2013.07.28 18:37:56] [0014m.46s.593ms] [1] SC[11]: Registered sub-client [JobPrefsDBPI_33272515] with ID [1] for session ID [11] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:56] [0014m.46s.609ms] [1] CMT: There are [2] clients now: 4, 11
[2013.07.28 18:37:56] [0014m.46s.609ms] [1] SC[11]: UnRegistered sub-client [JobPrefsDBPI_33272515] with ID [1] for session ID [11] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:56] [0014m.46s.718ms] [1] CMT: Removed client [11]
[2013.07.28 18:37:56] [0014m.46s.718ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:56] [0014m.47s.187ms] [0] IT: Session [12] for host [CAD0] user [lev] with process ID [3024] created
[2013.07.28 18:37:56] [0014m.47s.187ms] [1] SC[12]: Registered sub-client [JobPrefsDBPI_33273093] with ID [1] for session ID [12] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:56] [0014m.47s.218ms] [1] SC[12]: Registered sub-client [JobPrefsDBPI_33273171] with ID [2] for session ID [12] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:56] [0014m.47s.234ms] [1] SC[12]: UnRegistered sub-client [JobPrefsDBPI_33273093] with ID [1] for session ID [12] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:56] [0014m.47s.234ms] [1] SC[12]: UnRegistered sub-client [JobPrefsDBPI_33273171] with ID [2] for session ID [12] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:56] [0014m.47s.265ms] [1] CMT: There are [2] clients now: 4, 12
[2013.07.28 18:37:56] [0014m.47s.265ms] [1] CMT: Removed client [12]
[2013.07.28 18:37:56] [0014m.47s.265ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:57] [0014m.47s.765ms] [0] IT: Session [13] for host [CAD0] user [lev] with process ID [3024] created
[2013.07.28 18:37:57] [0014m.47s.765ms] [1] SC[13]: Registered sub-client [JobPrefsDBPI_33273671] with ID [1] for session ID [13] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:57] [0014m.47s.812ms] [1] CMT: There are [2] clients now: 4, 13
[2013.07.28 18:37:57] [0014m.47s.828ms] [1] SC[13]: Registered sub-client [JobPrefsDBPI_33273765] with ID [2] for session ID [13] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:57] [0014m.48s.031ms] [1] SC[13]: UnRegistered sub-client [JobPrefsDBPI_33273765] with ID [2] for session ID [13] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:57] [0014m.48s.031ms] [1] SC[13]: UnRegistered sub-client [JobPrefsDBPI_33273671] with ID [1] for session ID [13] host [CAD0] user [lev] process ID [3024]
[2013.07.28 18:37:57] [0014m.48s.140ms] [1] CMT: Removed client [13]
[2013.07.28 18:37:57] [0014m.48s.140ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:37:58] [0014m.48s.312ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33274265] with ID [19] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:37:58] [0014m.48s.328ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33274265] with ID [19] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:03] [0014m.53s.453ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33279406] with ID [20] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:03] [0014m.53s.468ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33279406] with ID [20] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:03] [0014m.53s.546ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33279484] with ID [21] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:03] [0014m.53s.562ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33279484] with ID [21] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:03] [0014m.53s.906ms] [0] IT: Session [14] for host [CAD0] user [lev] with process ID [5472] created
[2013.07.28 18:38:03] [0014m.53s.906ms] [1] SC[14]: Registered sub-client [JobPrefsDBPI_33279828] with ID [1] for session ID [14] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:03] [0014m.53s.921ms] [1] SC[14]: UnRegistered sub-client [JobPrefsDBPI_33279828] with ID [1] for session ID [14] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:03] [0014m.53s.937ms] [1] CMT: There are [2] clients now: 4, 14
[2013.07.28 18:38:03] [0014m.53s.937ms] [1] CMT: Removed client [14]
[2013.07.28 18:38:03] [0014m.53s.937ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:38:04] [0014m.54s.500ms] [0] IT: Session [15] for host [CAD0] user [lev] with process ID [5472] created
[2013.07.28 18:38:04] [0014m.54s.500ms] [1] SC[15]: Registered sub-client [JobPrefsDBPI_33280421] with ID [1] for session ID [15] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.54s.531ms] [1] SC[15]: Registered sub-client [JobPrefsDBPI_33280484] with ID [2] for session ID [15] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.54s.546ms] [1] SC[15]: UnRegistered sub-client [JobPrefsDBPI_33280421] with ID [1] for session ID [15] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.54s.546ms] [1] SC[15]: UnRegistered sub-client [JobPrefsDBPI_33280484] with ID [2] for session ID [15] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.54s.593ms] [1] CMT: There are [2] clients now: 4, 15
[2013.07.28 18:38:04] [0014m.54s.593ms] [1] CMT: Removed client [15]
[2013.07.28 18:38:04] [0014m.54s.593ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:38:04] [0014m.55s.062ms] [0] IT: Session [16] for host [CAD0] user [lev] with process ID [5472] created
[2013.07.28 18:38:04] [0014m.55s.062ms] [1] SC[16]: Registered sub-client [JobPrefsDBPI_33280984] with ID [1] for session ID [16] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.55s.125ms] [1] SC[16]: Registered sub-client [JobPrefsDBPI_33281062] with ID [2] for session ID [16] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.55s.140ms] [1] CMT: There are [2] clients now: 4, 16
[2013.07.28 18:38:04] [0014m.55s.203ms] [1] SC[16]: UnRegistered sub-client [JobPrefsDBPI_33281062] with ID [2] for session ID [16] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.55s.203ms] [1] SC[16]: UnRegistered sub-client [JobPrefsDBPI_33280984] with ID [1] for session ID [16] host [CAD0] user [lev] process ID [5472]
[2013.07.28 18:38:04] [0014m.55s.250ms] [1] CMT: Removed client [16]
[2013.07.28 18:38:04] [0014m.55s.250ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:38:05] [0014m.55s.609ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33281562] with ID [22] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:05] [0014m.55s.625ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33281562] with ID [22] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:29] [0015m.20s.062ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33306015] with ID [23] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:29] [0015m.20s.078ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33306015] with ID [23] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:29] [0015m.20s.125ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33306062] with ID [24] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:29] [0015m.20s.140ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33306062] with ID [24] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:30] [0015m.20s.609ms] [0] IT: Session [17] for host [CAD0] user [lev] with process ID [6120] created
[2013.07.28 18:38:30] [0015m.20s.609ms] [1] SC[17]: Registered sub-client [JobPrefsDBPI_33306531] with ID [1] for session ID [17] host [CAD0] user [lev] process ID [6120]
[2013.07.28 18:38:30] [0015m.20s.625ms] [1] CMT: There are [2] clients now: 4, 17
[2013.07.28 18:38:30] [0015m.20s.625ms] [1] SC[17]: UnRegistered sub-client [JobPrefsDBPI_33306531] with ID [1] for session ID [17] host [CAD0] user [lev] process ID [6120]
[2013.07.28 18:38:30] [0015m.20s.734ms] [1] CMT: Removed client [17]
[2013.07.28 18:38:30] [0015m.20s.734ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:38:30] [0015m.21s.171ms] [0] IT: Session [18] for host [CAD0] user [lev] with process ID [6120] created
[2013.07.28 18:38:30] [0015m.21s.171ms] [1] SC[18]: Registered sub-client [JobPrefsDBPI_33307093] with ID [1] for session ID [18] host [CAD0] user [lev] process ID [6120]
[2013.07.28 18:38:30] [0015m.21s.234ms] [1] SC[18]: Registered sub-client [JobPrefsDBPI_33307171] with ID [2] for session ID [18] host [CAD0] user [lev] process ID [6120]
[2013.07.28 18:38:30] [0015m.21s.281ms] [1] CMT: There are [2] clients now: 4, 18
[2013.07.28 18:38:31] [0015m.21s.296ms] [1] SC[18]: UnRegistered sub-client [JobPrefsDBPI_33307171] with ID [2] for session ID [18] host [CAD0] user [lev] process ID [6120]
[2013.07.28 18:38:31] [0015m.21s.312ms] [1] SC[18]: UnRegistered sub-client [JobPrefsDBPI_33307093] with ID [1] for session ID [18] host [CAD0] user [lev] process ID [6120]
[2013.07.28 18:38:31] [0015m.21s.390ms] [1] CMT: Removed client [18]
[2013.07.28 18:38:31] [0015m.21s.390ms] [1] CMT: There are [1] clients now: 4
[2013.07.28 18:38:31] [0015m.21s.734ms] [1] SC[4]: Registered sub-client [JobPrefsDBPI_33307671] with ID [25] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:31] [0015m.21s.750ms] [1] SC[4]: UnRegistered sub-client [JobPrefsDBPI_33307671] with ID [25] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:42] [0015m.32s.859ms] [1] SC[4]: UnRegistered sub-client [Expedition PCB_32385906] with ID [1] for session ID [4] host [CAD0] user [lev] process ID [4124]
[2013.07.28 18:38:42] [0015m.32s.875ms] [1] CMT: Removed client [4]
[2013.07.28 18:38:42] [0015m.32s.875ms] [1] CMT: There are no clients left - waiting [1 seconds]
[2013.07.28 18:38:44] [0015m.34s.296ms] [0] CMT: Starting server auto-close
[2013.07.28 18:38:44] [0015m.34s.312ms] [0] S: Closing server
[2013.07.28 18:38:44] [0015m.34s.453ms] [0] iCDB Server PI: Closing plugins
[2013.07.28 18:38:44] [0015m.34s.453ms] [0] iCDB Server PI: Plugins closed
[2013.07.28 18:38:44] [0015m.34s.453ms] [0] iCDB Server PI: Unloading database
[2013.07.28 18:38:44] [0015m.34s.453ms] [0] iCDB Server PI: Saving storage
[2013.07.28 18:38:44] [0015m.34s.453ms] [0] iCDB Server PI: Closing database
[2013.07.28 18:38:44] [0015m.34s.453ms] [1] iCDB Server PI: Stats: Database defragmentation: max[4] avg[1] holes[27%] data[93%]
[2013.07.28 18:38:44] [0015m.34s.453ms] [1] iCDB Server PI: Stats: Database file size [60744 (59.3 kB)]
[2013.07.28 18:38:44] [0015m.34s.453ms] [1] iCDB Server PI: WARNING: Database needs defragmentation!
[2013.07.28 18:38:44] [0015m.34s.546ms] [0] iCDB Server PI: Database closed
[2013.07.28 18:38:44] [0015m.34s.546ms] [0] iCDB Server PI: Defragmenting database
[2013.07.28 18:38:44] [0015m.34s.562ms] [0] iCDB Server PI: Creating database [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb] backup to file [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb\cdbback\2013-07-28 18.38.44-3324-d.zip]
[2013.07.28 18:38:44] [0015m.34s.578ms] [0] iCDB Server PI: Database backup: DONE
[2013.07.28 18:38:44] [0015m.34s.609ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2013.07.28 18:38:44] [0015m.34s.609ms] [0] Database GUARD OK: [60744]
[2013.07.28 18:38:44] [0015m.34s.609ms] [0] SingleFile: [1e10-38a3-6df9-d43f] SFI version check [1009] [1009]
[2013.07.28 18:38:44] [0015m.34s.609ms] [0] SingleFile: [1e10-38a3-6df9-d43f] Database SFI header has been read in [2ms 117us]
[2013.07.28 18:38:44] [0015m.34s.625ms] [1] iCDB Server PI: Stats: Database file sizes: before[60744 (59.3 kB)], after[50352 (49.2 kB)], gain[10392 (10.1 kB)]
[2013.07.28 18:38:44] [0015m.34s.640ms] [0] Single file [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb\icdb.dat] closed with size [50352 (49.2 kB)]
[2013.07.28 18:38:44] [0015m.34s.640ms] [0] iCDB Server PI: Database defragmentation completed successfully
[2013.07.28 18:38:44] [0015m.34s.640ms] [1] BackupTransaction: Removing database backup [Y:\Boards\VB\NEW_Project\PCB\keyin.icdb\cdbback\2013-07-28 18.38.44-3324-d.zip]
[2013.07.28 18:38:44] [0015m.34s.640ms] [1] iCDB Server PI: Stats: Total iCDB execution time: [22867091] ticks
[2013.07.28 18:38:44] [0015m.34s.640ms] [1] iCDB Server PI: Stats: Total iCDB execution time: [7221] microseconds
[2013.07.28 18:38:44] [0015m.34s.640ms] [1] iCDB Server PI: Stats: Total iCDB commands count: [146]
[2013.07.28 18:38:44] [0015m.34s.640ms] [1] iCDB Server PI: Stats: Average iCDB speed:        [20218] commands per second
[2013.07.28 18:38:44] [0015m.34s.843ms] [0] S: STOP
